[INFO] fetching crate catj 0.2.3...
[INFO] testing catj-0.2.3 against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2
[INFO] extracting crate catj 0.2.3 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate catj 0.2.3
[INFO] finished tweaking crates.io crate catj 0.2.3
[INFO] tweaked toml for crates.io crate catj 0.2.3 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate catj 0.2.3 on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate catj 0.2.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8
[INFO] running `Command { std: "docker" "start" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.68
[INFO] [stderr]    Compiling unicode-ident v1.0.5
[INFO] [stderr]    Compiling libc v0.2.148
[INFO] [stderr]    Compiling syn v1.0.103
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling memoffset v0.7.1
[INFO] [stderr]    Compiling rustix v0.38.17
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling linux-raw-sys v0.4.8
[INFO] [stderr]    Compiling thiserror v1.0.38
[INFO] [stderr]    Compiling cc v1.0.78
[INFO] [stderr]    Compiling regex-syntax v0.6.28
[INFO] [stderr]    Compiling anstyle-parse v0.2.2
[INFO] [stderr]    Compiling anstyle v1.0.4
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling cvt v0.1.2
[INFO] [stderr]    Compiling once_cell v1.17.0
[INFO] [stderr]    Compiling clap_lex v0.5.1
[INFO] [stderr]    Compiling iana-time-zone v0.1.53
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling anstream v0.6.4
[INFO] [stderr]    Compiling heck v0.4.0
[INFO] [stderr]    Compiling path-dedot v3.1.1
[INFO] [stderr]    Compiling normpath v1.1.1
[INFO] [stderr]    Compiling glob v0.3.1
[INFO] [stderr]    Compiling nu-ansi-term v0.49.0
[INFO] [stderr]    Compiling fastrand v2.0.1
[INFO] [stderr]    Compiling path-absolutize v3.1.1
[INFO] [stderr]    Compiling clap_builder v4.4.6
[INFO] [stderr]    Compiling aho-corasick v0.7.20
[INFO] [stderr]    Compiling libc-stdhandle v0.1.0
[INFO] [stderr]    Compiling quote v1.0.33
[INFO] [stderr]    Compiling chrono v0.4.31
[INFO] [stderr]    Compiling syn v2.0.38
[INFO] [stderr]    Compiling regex v1.7.0
[INFO] [stderr]    Compiling nix v0.26.4
[INFO] [stderr]    Compiling nix v0.25.1
[INFO] [stderr]    Compiling is-terminal v0.4.9
[INFO] [stderr]    Compiling tempfile v3.8.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.38
[INFO] [stderr]    Compiling clap_derive v4.4.2
[INFO] [stderr]    Compiling cgroups-rs v0.3.3
[INFO] [stderr]    Compiling flexi_logger v0.27.2
[INFO] [stderr]    Compiling clap v4.4.6
[INFO] [stderr]    Compiling fs_at v0.1.10
[INFO] [stderr]    Compiling remove_dir_all v0.8.2
[INFO] [stderr]    Compiling catj v0.2.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stdout]  --> src/utils/mod.rs:8:28
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stdout]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: irrefutable `if let` pattern
[INFO] [stdout]    --> src/catbox.rs:433:10
[INFO] [stdout]     |
[INFO] [stdout] 433 |       if let Err(e) = result {
[INFO] [stdout]     |          ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: this pattern will always match, so the `if let` is useless
[INFO] [stdout]     = help: consider replacing the `if let` with a `let`
[INFO] [stdout]     = note: `#[warn(irrefutable_let_patterns)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `result`
[INFO] [stdout]    --> src/context/mod.rs:285:45
[INFO] [stdout]     |
[INFO] [stdout] 285 |   fn add_result(&mut self, _label: &String, result: CatBoxResult) -> bool {
[INFO] [stdout]     |                                             ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/context/mod.rs:115:19
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<CatBoxOption> {
[INFO] [stdout]     |                   ^^^^^     ^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |                   |
[INFO] [stdout]     |                   the lifetime is elided here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<'_, CatBoxOption> {
[INFO] [stdout]     |                                  +++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `command`
[INFO] [stdout]  --> src/main.rs:6:12
[INFO] [stdout]   |
[INFO] [stdout] 6 | use clap::{command, Parser, Subcommand};
[INFO] [stdout]   |            ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `CatBoxOptionBuilder`
[INFO] [stdout]   --> src/context/mod.rs:12:34
[INFO] [stdout]    |
[INFO] [stdout] 12 | pub use builder::{CatBoxBuilder, CatBoxOptionBuilder};
[INFO] [stdout]    |                                  ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stdout]  --> src/utils/mod.rs:8:28
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stdout]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: irrefutable `if let` pattern
[INFO] [stdout]    --> src/catbox.rs:433:10
[INFO] [stdout]     |
[INFO] [stdout] 433 |       if let Err(e) = result {
[INFO] [stdout]     |          ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: this pattern will always match, so the `if let` is useless
[INFO] [stdout]     = help: consider replacing the `if let` with a `let`
[INFO] [stdout]     = note: `#[warn(irrefutable_let_patterns)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `result`
[INFO] [stdout]    --> src/context/mod.rs:285:45
[INFO] [stdout]     |
[INFO] [stdout] 285 |   fn add_result(&mut self, _label: &String, result: CatBoxResult) -> bool {
[INFO] [stdout]     |                                             ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]    --> src/preset/preset.rs:143:36
[INFO] [stdout]     |
[INFO] [stdout] 143 |   pub(crate) fn append_write_mount(mut self) -> Self {
[INFO] [stdout]     |                                    ----^^^^
[INFO] [stdout]     |                                    |
[INFO] [stdout]     |                                    help: remove this `mut`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/context/mod.rs:115:19
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<CatBoxOption> {
[INFO] [stdout]     |                   ^^^^^     ^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |                   |
[INFO] [stdout]     |                   the lifetime is elided here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<'_, CatBoxOption> {
[INFO] [stdout]     |                                  +++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 27.75s
[INFO] running `Command { std: "docker" "inspect" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stdout]  --> src/utils/mod.rs:8:28
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stdout]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: irrefutable `if let` pattern
[INFO] [stdout]    --> src/catbox.rs:433:10
[INFO] [stdout]     |
[INFO] [stdout] 433 |       if let Err(e) = result {
[INFO] [stdout]     |          ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: this pattern will always match, so the `if let` is useless
[INFO] [stdout]     = help: consider replacing the `if let` with a `let`
[INFO] [stdout]     = note: `#[warn(irrefutable_let_patterns)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `result`
[INFO] [stdout]    --> src/context/mod.rs:285:45
[INFO] [stdout]     |
[INFO] [stdout] 285 |   fn add_result(&mut self, _label: &String, result: CatBoxResult) -> bool {
[INFO] [stdout]     |                                             ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/context/mod.rs:115:19
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<CatBoxOption> {
[INFO] [stdout]     |                   ^^^^^     ^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |                   |
[INFO] [stdout]     |                   the lifetime is elided here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<'_, CatBoxOption> {
[INFO] [stdout]     |                                  +++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling catj v0.2.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `command`
[INFO] [stdout]  --> src/main.rs:6:12
[INFO] [stdout]   |
[INFO] [stdout] 6 | use clap::{command, Parser, Subcommand};
[INFO] [stdout]   |            ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `CatBoxOptionBuilder`
[INFO] [stdout]   --> src/context/mod.rs:12:34
[INFO] [stdout]    |
[INFO] [stdout] 12 | pub use builder::{CatBoxBuilder, CatBoxOptionBuilder};
[INFO] [stdout]    |                                  ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stdout]  --> src/utils/mod.rs:8:28
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stdout]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: irrefutable `if let` pattern
[INFO] [stdout]    --> src/catbox.rs:433:10
[INFO] [stdout]     |
[INFO] [stdout] 433 |       if let Err(e) = result {
[INFO] [stdout]     |          ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: this pattern will always match, so the `if let` is useless
[INFO] [stdout]     = help: consider replacing the `if let` with a `let`
[INFO] [stdout]     = note: `#[warn(irrefutable_let_patterns)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `result`
[INFO] [stdout]    --> src/context/mod.rs:285:45
[INFO] [stdout]     |
[INFO] [stdout] 285 |   fn add_result(&mut self, _label: &String, result: CatBoxResult) -> bool {
[INFO] [stdout]     |                                             ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]    --> src/preset/preset.rs:143:36
[INFO] [stdout]     |
[INFO] [stdout] 143 |   pub(crate) fn append_write_mount(mut self) -> Self {
[INFO] [stdout]     |                                    ----^^^^
[INFO] [stdout]     |                                    |
[INFO] [stdout]     |                                    help: remove this `mut`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/context/mod.rs:115:19
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<CatBoxOption> {
[INFO] [stdout]     |                   ^^^^^     ^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |                   |
[INFO] [stdout]     |                   the lifetime is elided here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<'_, CatBoxOption> {
[INFO] [stdout]     |                                  +++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `command`
[INFO] [stdout]  --> src/main.rs:6:12
[INFO] [stdout]   |
[INFO] [stdout] 6 | use clap::{command, Parser, Subcommand};
[INFO] [stdout]   |            ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `CatBoxOptionBuilder`
[INFO] [stdout]   --> src/context/mod.rs:12:34
[INFO] [stdout]    |
[INFO] [stdout] 12 | pub use builder::{CatBoxBuilder, CatBoxOptionBuilder};
[INFO] [stdout]    |                                  ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stdout]  --> src/utils/mod.rs:8:28
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stdout]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stdout]  --> src/utils/mod.rs:8:28
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stdout]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: irrefutable `if let` pattern
[INFO] [stdout]    --> src/catbox.rs:433:10
[INFO] [stdout]     |
[INFO] [stdout] 433 |       if let Err(e) = result {
[INFO] [stdout]     |          ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: this pattern will always match, so the `if let` is useless
[INFO] [stdout]     = help: consider replacing the `if let` with a `let`
[INFO] [stdout]     = note: `#[warn(irrefutable_let_patterns)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: irrefutable `if let` pattern
[INFO] [stdout]    --> src/catbox.rs:433:10
[INFO] [stdout]     |
[INFO] [stdout] 433 |       if let Err(e) = result {
[INFO] [stdout]     |          ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: this pattern will always match, so the `if let` is useless
[INFO] [stdout]     = help: consider replacing the `if let` with a `let`
[INFO] [stdout]     = note: `#[warn(irrefutable_let_patterns)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `result`
[INFO] [stdout]    --> src/context/mod.rs:285:45
[INFO] [stdout]     |
[INFO] [stdout] 285 |   fn add_result(&mut self, _label: &String, result: CatBoxResult) -> bool {
[INFO] [stdout]     |                                             ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]    --> src/preset/preset.rs:143:36
[INFO] [stdout]     |
[INFO] [stdout] 143 |   pub(crate) fn append_write_mount(mut self) -> Self {
[INFO] [stdout]     |                                    ----^^^^
[INFO] [stdout]     |                                    |
[INFO] [stdout]     |                                    help: remove this `mut`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `result`
[INFO] [stdout]    --> src/context/mod.rs:285:45
[INFO] [stdout]     |
[INFO] [stdout] 285 |   fn add_result(&mut self, _label: &String, result: CatBoxResult) -> bool {
[INFO] [stdout]     |                                             ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/context/mod.rs:115:19
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<CatBoxOption> {
[INFO] [stdout]     |                   ^^^^^     ^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |                   |
[INFO] [stdout]     |                   the lifetime is elided here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<'_, CatBoxOption> {
[INFO] [stdout]     |                                  +++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stdout]    --> src/context/mod.rs:115:19
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<CatBoxOption> {
[INFO] [stdout]     |                   ^^^^^     ^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stdout]     |                   |
[INFO] [stdout]     |                   the lifetime is elided here
[INFO] [stdout]     |
[INFO] [stdout]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stdout]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stdout] help: use `'_` for type paths
[INFO] [stdout]     |
[INFO] [stdout] 115 |   pub fn commands(&self) -> Iter<'_, CatBoxOption> {
[INFO] [stdout]     |                                  +++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.69s
[INFO] running `Command { std: "docker" "inspect" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stderr]  --> src/utils/mod.rs:8:28
[INFO] [stderr]   |
[INFO] [stderr] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stderr]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: irrefutable `if let` pattern
[INFO] [stderr]    --> src/catbox.rs:433:10
[INFO] [stderr]     |
[INFO] [stderr] 433 |       if let Err(e) = result {
[INFO] [stderr]     |          ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: this pattern will always match, so the `if let` is useless
[INFO] [stderr]     = help: consider replacing the `if let` with a `let`
[INFO] [stderr]     = note: `#[warn(irrefutable_let_patterns)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `result`
[INFO] [stderr]    --> src/context/mod.rs:285:45
[INFO] [stderr]     |
[INFO] [stderr] 285 |   fn add_result(&mut self, _label: &String, result: CatBoxResult) -> bool {
[INFO] [stderr]     |                                             ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing
[INFO] [stderr]    --> src/context/mod.rs:115:19
[INFO] [stderr]     |
[INFO] [stderr] 115 |   pub fn commands(&self) -> Iter<CatBoxOption> {
[INFO] [stderr]     |                   ^^^^^     ^^^^^^^^^^^^^^^^^^ the same lifetime is hidden here
[INFO] [stderr]     |                   |
[INFO] [stderr]     |                   the lifetime is elided here
[INFO] [stderr]     |
[INFO] [stderr]     = help: the same lifetime is referred to in inconsistent ways, making the signature confusing
[INFO] [stderr]     = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default
[INFO] [stderr] help: use `'_` for type paths
[INFO] [stderr]     |
[INFO] [stderr] 115 |   pub fn commands(&self) -> Iter<'_, CatBoxOption> {
[INFO] [stderr]     |                                  +++
[INFO] [stderr] 
[INFO] [stderr] warning: `catj` (lib) generated 4 warnings (run `cargo fix --lib -p catj` to apply 3 suggestions)
[INFO] [stderr] warning: `catj` (lib test) generated 4 warnings (4 duplicates)
[INFO] [stderr] warning: unused import: `command`
[INFO] [stderr]  --> src/main.rs:6:12
[INFO] [stderr]   |
[INFO] [stderr] 6 | use clap::{command, Parser, Subcommand};
[INFO] [stderr]   |            ^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `CatBoxOptionBuilder`
[INFO] [stderr]   --> src/context/mod.rs:12:34
[INFO] [stderr]    |
[INFO] [stderr] 12 | pub use builder::{CatBoxBuilder, CatBoxOptionBuilder};
[INFO] [stderr]    |                                  ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused imports: `CatBoxReadPipe` and `CatBoxWritePipe`
[INFO] [stderr]  --> src/utils/mod.rs:8:28
[INFO] [stderr]   |
[INFO] [stderr] 8 | pub use pipe::{CatBoxPipe, CatBoxReadPipe, CatBoxWritePipe};
[INFO] [stderr]   |                            ^^^^^^^^^^^^^^  ^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: variable does not need to be mutable
[INFO] [stderr]    --> src/preset/preset.rs:143:36
[INFO] [stderr]     |
[INFO] [stderr] 143 |   pub(crate) fn append_write_mount(mut self) -> Self {
[INFO] [stderr]     |                                    ----^^^^
[INFO] [stderr]     |                                    |
[INFO] [stderr]     |                                    help: remove this `mut`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `catj` (bin "catj") generated 7 warnings (3 duplicates) (run `cargo fix --bin "catj" -p catj` to apply 4 suggestions)
[INFO] [stderr] warning: `catj` (bin "catj" test) generated 7 warnings (7 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/catj-c09c628aa4b433c0)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/catj-019f7e13bf4ce26e)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running tests/aplusb.rs (/opt/rustwide/target/debug/deps/aplusb-5de711485973bd4e)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stderr] INFO [aplusb] Start running while1.c at /tmp/.tmpTLhmE9
[INFO] [stderr] INFO [aplusb] Start running big_stack.cpp at /tmp/.tmpsLnvW3
[INFO] [stderr] INFO [aplusb] Start running assert.cpp at /tmp/.tmp0ANoHQ
[INFO] [stderr] INFO [aplusb] Start running malloc.c at /tmp/.tmpp0T05u
[INFO] [stderr] INFO [aplusb] Start running ac.cpp at /tmp/.tmpUIsdgp
[INFO] [stderr] INFO [aplusb] Start running fork.cpp at /tmp/.tmpeoAMN8
[INFO] [stderr] INFO [aplusb] Start running uid.c at /tmp/.tmpUW2l3k
[INFO] [stderr] INFO [aplusb] Start running re2.c at /tmp/.tmpKiKB5u
[INFO] [stderr] INFO [aplusb] Start running output_size.c at /tmp/.tmpV2CwNY
[INFO] [stderr] INFO [aplusb] Start running env.c at /tmp/.tmpPSM2mX
[INFO] [stderr] INFO [aplusb] Start running mle.cpp at /tmp/.tmpWx6kQR
[INFO] [stderr] INFO [aplusb] Start running tle.cpp at /tmp/.tmpUJvhpW
[INFO] [stderr] INFO [aplusb] Start running sleep.c at /tmp/.tmpeC8reh
[INFO] [stderr] INFO [aplusb] Start running small_stack.cpp at /tmp/.tmpXV7ZR3
[INFO] [stderr] INFO [aplusb] Start running re1.c at /tmp/.tmpQWEj0z
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpJjWE3z
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/re1.c -o /tmp/.tmpQWEj0z/Main.out -lm
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmppbVXCA
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/re2.c -o /tmp/.tmpKiKB5u/Main.out -lm
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpXUpKaU
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/env.c -o /tmp/.tmpPSM2mX/Main.out -lm
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpTEETjj
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/uid.c -o /tmp/.tmpUW2l3k/Main.out -lm
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpOIwwmz
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/sleep.c -o /tmp/.tmpeC8reh/Main.out -lm
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpP0Jo1S
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program g++ ./fixtures/aplusb/source/assert.cpp -o /tmp/.tmp0ANoHQ/Main.out -lm
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpN7IogC
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program g++ ./fixtures/aplusb/source/mle.cpp -o /tmp/.tmpWx6kQR/Main.out -lm
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpqKlNNT
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/while1.c -o /tmp/.tmpTLhmE9/Main.out -lm
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpcOPxp9
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpiYSOJO
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/output_size.c -o /tmp/.tmpV2CwNY/Main.out -lm
[INFO] [stderr] INFO [catj::catbox] Start running program gcc ./fixtures/aplusb/source/malloc.c -o /tmp/.tmpp0T05u/Main.out -lm
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpqzmach
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program g++ ./fixtures/aplusb/source/big_stack.cpp -o /tmp/.tmpsLnvW3/Main.out -lm
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1265
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1255
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1263
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1266
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1254
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1269
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpZKameC
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program g++ ./fixtures/aplusb/source/fork.cpp -o /tmp/.tmpeoAMN8/Main.out -lm
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1256
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1259
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1268
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1274
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpBpCdc6
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program g++ ./fixtures/aplusb/source/small_stack.cpp -o /tmp/.tmpXV7ZR3/Main.out -lm
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpOl0aFj
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program g++ ./fixtures/aplusb/source/tle.cpp -o /tmp/.tmpUJvhpW/Main.out -lm
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Mount new root: /tmp/.tmpdZN4Kq
[INFO] [stderr] ERROR [catj::catbox] Chroot fails: CatBox Nix Error: EPERM: Operation not permitted
[INFO] [stderr] INFO [catj::catbox] Set alarm 11 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program g++ ./fixtures/aplusb/source/ac.cpp -o /tmp/.tmpUIsdgp/Main.out -lm
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1262
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1275
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1277
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1278
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1279
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1262. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.035221 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.026088 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 19812
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 61, time_user: 35, time_sys: 26, memory: 19812 }
[INFO] [stderr] INFO [aplusb] Compile sleep.c -> /tmp/.tmpeC8reh/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process #1255. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.083522 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.050875 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 19812
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 134, time_user: 83, time_sys: 50, memory: 19812 }
[INFO] [stderr] INFO [aplusb] Compile re2.c -> /tmp/.tmpKiKB5u/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process #1254. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.110076 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.076889 seconds
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 19812
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 186, time_user: 110, time_sys: 76, memory: 19812 }
[INFO] [stderr] INFO [aplusb] Compile re1.c -> /tmp/.tmpQWEj0z/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process #1277. exited with status 0
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.155636 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.110627 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 266, time_user: 155, time_sys: 110, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile small_stack.cpp -> /tmp/.tmpXV7ZR3/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process #1274. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.205698 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.141678 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 347, time_user: 205, time_sys: 141, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile big_stack.cpp -> /tmp/.tmpsLnvW3/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1309
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1303
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1299
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1303. is stopped by SIGSEGV
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1304
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1305
[INFO] [stderr] INFO [catj::catbox] Child process #1268. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.239564 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.161996 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 401, time_user: 239, time_sys: 161, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile while1.c -> /tmp/.tmpTLhmE9/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1310
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1259. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.281234 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.192874 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 474, time_user: 281, time_sys: 192, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile uid.c -> /tmp/.tmpUW2l3k/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process #1304. exited with status 42
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.283829 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.192874 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 476, time_user: 283, time_sys: 192, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Running re1.c ok at /tmp/.tmpQWEj0z
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1316
[INFO] [stdout] test it_should_not_run_re1 ... ok
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1275. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.335977 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.226474 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stdout] test it_should_run_uid ... ok
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 562, time_user: 335, time_sys: 226, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile fork.cpp -> /tmp/.tmpeoAMN8/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Child process #1316. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.337487 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.227983 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 565, time_user: 337, time_sys: 227, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Running uid.c ok at /tmp/.tmpUW2l3k
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1321
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1321. is stopped for forbidden syscall (id = 435)
[INFO] [stderr] INFO [catj::catbox] Child process #1321. is signaled by SIGKILL
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.337487 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.230565 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 568, time_user: 337, time_sys: 230, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Running fork.cpp ok at /tmp/.tmpeoAMN8
[INFO] [stdout] test it_should_not_run_fork ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1256. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.376374 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.261475 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 637, time_user: 376, time_sys: 261, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile env.c -> /tmp/.tmpPSM2mX/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process #1266. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.427934 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.288016 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 715, time_user: 427, time_sys: 288, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile malloc.c -> /tmp/.tmpp0T05u/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process #1303. is signaled by SIGSEGV
[INFO] [stdout] test it_should_not_run_re2 ... ok
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.427934 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.290853 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 718, time_user: 427, time_sys: 290, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Running re2.c ok at /tmp/.tmpKiKB5u
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1325
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1326
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1325. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.427934 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.293549 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 721, time_user: 427, time_sys: 293, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Running env.c ok at /tmp/.tmpPSM2mX
[INFO] [stdout] test it_should_not_run_env ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1269. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.469187 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.329881 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 23640
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 799, time_user: 469, time_sys: 329, memory: 23640 }
[INFO] [stderr] INFO [aplusb] Compile output_size.c -> /tmp/.tmpV2CwNY/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Child process #1305. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.483186 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.420870 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 83604
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 904, time_user: 483, time_sys: 420, memory: 83604 }
[INFO] [stderr] INFO [aplusb] Testcase #1. out: 2
[INFO] [stderr] INFO [aplusb] Testcase #1. ans: 2
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1327
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1328
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1328. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.497214 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.510052 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 83604
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 1007, time_user: 497, time_sys: 510, memory: 83604 }
[INFO] [stderr] INFO [aplusb] Testcase #2. out: 1000000001
[INFO] [stderr] INFO [aplusb] Testcase #2. ans: 1000000001
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1332
[INFO] [stderr] INFO [catj::catbox] Child process #1326. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.542256 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.729385 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 1271, time_user: 542, time_sys: 729, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Running malloc.c ok at /tmp/.tmpp0T05u
[INFO] [stdout] test it_should_not_run_malloc ... ok
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1332. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.563807 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.801875 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 1365, time_user: 563, time_sys: 801, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Testcase #3. out: 100001
[INFO] [stderr] INFO [aplusb] Testcase #3. ans: 100001
[INFO] [stderr] INFO [aplusb] Running small_stack.cpp ok at /tmp/.tmpXV7ZR3
[INFO] [stdout] test it_should_run_small_stack ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1279. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 1.055034 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.907774 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 1962, time_user: 1055, time_sys: 907, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Compile ac.cpp -> /tmp/.tmpUIsdgp/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1336
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1336. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 1.055034 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.911830 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 1966, time_user: 1055, time_sys: 911, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Testcase #1. out: 2
[INFO] [stderr] INFO [aplusb] Testcase #1. ans: 2
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1340
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1340. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 1.055034 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.916274 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 1971, time_user: 1055, time_sys: 916, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Testcase #2. out: 1000000001
[INFO] [stderr] INFO [aplusb] Testcase #2. ans: 1000000001
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Child process #1265. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 1.543825 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 1.009014 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 2552, time_user: 1543, time_sys: 1009, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Compile mle.cpp -> /tmp/.tmpWx6kQR/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1341
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1342
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1341. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 1.545004 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 1.012550 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 2557, time_user: 1545, time_sys: 1012, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Testcase #3. out: 100001
[INFO] [stderr] INFO [aplusb] Testcase #3. ans: 100001
[INFO] [stderr] INFO [aplusb] Running ac.cpp ok at /tmp/.tmpUIsdgp
[INFO] [stdout] test it_should_run_cpp_ac ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1263. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 2.058143 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 1.115254 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 3173, time_user: 2058, time_sys: 1115, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Compile assert.cpp -> /tmp/.tmp0ANoHQ/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1346
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1278. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 2.547697 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 1.214481 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 3762, time_user: 2547, time_sys: 1214, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Compile tle.cpp -> /tmp/.tmpUJvhpW/Main.out ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Child process #1346. is stopped by SIGABRT
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1347
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] INFO [catj::catbox] Child process #1346. is signaled by SIGABRT
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 2.549812 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 1.216966 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 3766, time_user: 2549, time_sys: 1216, memory: 263264 }
[INFO] [stdout] test it_should_not_run_assert ... ok
[INFO] [stderr] INFO [aplusb] Running assert.cpp ok at /tmp/.tmp0ANoHQ
[INFO] [stderr] INFO [catj::catbox] Child process #1299. is stopped by SIGALRM (may be time limit exceeded)
[INFO] [stdout] test it_should_not_run_sleep ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1299. is signaled by SIGALRM
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 2.549812 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 1.219365 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 3769, time_user: 2549, time_sys: 1219, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Running sleep.c ok at /tmp/.tmpeC8reh
[INFO] [stderr] INFO [catj::catbox] Child process #1309. is stopped by SIGALRM (may be time limit exceeded)
[INFO] [stderr] INFO [catj::catbox] Child process #1310. is stopped by SIGALRM (may be time limit exceeded)
[INFO] [stderr] INFO [catj::catbox] Child process #1310. is signaled by SIGALRM
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 3.350439 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 1.224264 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 263264
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 4574, time_user: 3350, time_sys: 1224, memory: 263264 }
[INFO] [stderr] INFO [aplusb] Running while1.c ok at /tmp/.tmpTLhmE9
[INFO] [stdout] test it_should_not_run_while1 ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1309. is signaled by SIGALRM
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 3.457229 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 2.172396 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 903740
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 5629, time_user: 3457, time_sys: 2172, memory: 903740 }
[INFO] [stderr] INFO [aplusb] Running big_stack.cpp ok at /tmp/.tmpsLnvW3
[INFO] [stdout] test it_should_not_run_big_stack ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1342. exited with status 0
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 3.952102 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 2.473837 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 903740
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 6425, time_user: 3952, time_sys: 2473, memory: 903740 }
[INFO] [stderr] INFO [aplusb] Running mle.cpp ok at /tmp/.tmpWx6kQR
[INFO] [stdout] test it_should_not_run_mle ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1347. is stopped by SIGALRM (may be time limit exceeded)
[INFO] [stderr] INFO [catj::catbox] Child process #1347. is signaled by SIGALRM
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 5.529991 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 2.477784 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 903740
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 8007, time_user: 5529, time_sys: 2477, memory: 903740 }
[INFO] [stderr] INFO [aplusb] Running tle.cpp ok at /tmp/.tmpUJvhpW
[INFO] [stdout] test it_should_not_run_tle ... ok
[INFO] [stderr] INFO [catj::catbox] Child process #1327. is stopped by SIGXFSZ
[INFO] [stderr] INFO [catj::catbox] Child process #1327. is signaled by SIGXFSZ
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 5.737871 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 3.595137 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 903740
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 9333, time_user: 5737, time_sys: 3595, memory: 903740 }
[INFO] [stderr] INFO [aplusb] Running output_size.c ok at /tmp/.tmpV2CwNY
[INFO] [stdout] test it_should_not_run_output_size ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.88s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/common.rs (/opt/rustwide/target/debug/deps/common-f16abed12d424836)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/run.rs (/opt/rustwide/target/debug/deps/run-cc03cf50f5af9bba)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test it_should_build_cat_box ... ok
[INFO] [stderr] INFO [catj::catbox] Child process is running
[INFO] [stderr] INFO [catj::catbox] Redirect child process IO ok
[INFO] [stderr] INFO [catj::catbox] Set alarm 2 seconds
[INFO] [stderr] INFO [catj::catbox] Start running program echo 123
[INFO] [stderr] INFO [catj::cgroup] Support cgroup subsystems: ["cpuset", "cpu", "blkio", "memory", "hugetlb", "pids", "freezer"]
[INFO] [stderr] INFO [catj::cgroup] Start initializing cgroup root/root.1352
[INFO] [stderr] ERROR [catj::cgroup] Build cgroup fails: fs error caused by: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stderr] DEBUG [catj::catbox] Start waiting for child process
[INFO] [stderr] echo: write error: Bad file descriptor
[INFO] [stderr] INFO [catj::catbox] Child process #1352. exited with status 1
[INFO] [stderr] DEBUG [catj::cgroup] usage.user_time: 0.001161 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.system_time: 0.002323 seconds
[INFO] [stderr] DEBUG [catj::cgroup] usage.max_rss: 3800
[INFO] [stderr] INFO [catj::catbox] CatBoxUsage { time: 3, time_user: 1, time_sys: 2, memory: 3800 }
[INFO] [stdout] test it_should_echo ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- it_should_echo stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'it_should_echo' (1351) panicked at tests/run.rs:26:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63c628db32e8 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63c628db32e8 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized::<std[d054f6f42beb1baa]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63c628db32e8 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63c628db32e8 - <<std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63c628dcaada - <core[5a1c3e9896636f3a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63c628dcaada - core[5a1c3e9896636f3a]::fmt::write
[INFO] [stdout]    6:     0x63c628db9482 - std[d054f6f42beb1baa]::io::default_write_fmt::<alloc[154f689e5dd3bae5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x63c628db9482 - <alloc[154f689e5dd3bae5]::vec::Vec<u8> as std[d054f6f42beb1baa]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x63c628d8fbb6 - <std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63c628d8fbb6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63c628daa769 - std[d054f6f42beb1baa]::panicking::default_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63c628a908dc - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   12:     0x63c628a908dc - test[fad20673b750c10e]::test_main_inner::<test[fad20673b750c10e]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x63c628daa922 - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   14:     0x63c628daa922 - std[d054f6f42beb1baa]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63c628d8fc72 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x63c628d872a9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace::<std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63c628d90b0d - __rustc[7ab284efd7f33ea8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63c628dcb2cc - core[5a1c3e9896636f3a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63c628dcb012 - core[5a1c3e9896636f3a]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1872:5
[INFO] [stdout]   20:     0x63c628a80da1 - <core[5a1c3e9896636f3a]::result::Result<alloc[154f689e5dd3bae5]::string::String, std[d054f6f42beb1baa]::io::error::Error>>::unwrap
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x63c628a80da1 - run[4ce31cc0a233e7db]::it_should_echo
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/run.rs:26:48
[INFO] [stdout]   22:     0x63c628a80667 - run[4ce31cc0a233e7db]::it_should_echo::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/run.rs:15:20
[INFO] [stdout]   23:     0x63c628a83856 - <run[4ce31cc0a233e7db]::it_should_echo::{closure#0} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63c628a839bb - <fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x63c628a839bb - test[fad20673b750c10e]::__rust_begin_short_backtrace::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x63c628a91235 - test[fad20673b750c10e]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x63c628a91235 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x63c628a91235 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x63c628a91235 - std[d054f6f42beb1baa]::panicking::catch_unwind::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x63c628a91235 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x63c628a91235 - test[fad20673b750c10e]::run_test_in_process
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x63c628a91235 - test[fad20673b750c10e]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x63c628a8bd94 - test[fad20673b750c10e]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x63c628a8bd94 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace::<test[fad20673b750c10e]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x63c628a942b2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x63c628a942b2 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x63c628a942b2 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x63c628a942b2 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x63c628a942b2 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x63c628a942b2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x63c628a942b2 - <std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x63c628db245f - <alloc[154f689e5dd3bae5]::boxed::Box<dyn core[5a1c3e9896636f3a]::ops::function::FnOnce<(), Output = ()> + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9
[INFO] [stdout]   43:     0x63c628db245f - <std[d054f6f42beb1baa]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7247f7535aa4 - <unknown>
[INFO] [stdout]   45:     0x7247f75c2a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     it_should_echo
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test run`
[INFO] running `Command { std: "docker" "inspect" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8", kill_on_drop: false }`
[INFO] [stdout] 3ae36b5886fe57386172ce237a67ea962361805d9f9972e27a3ca1701f9e18b8
